--------------------------------- Captured Out --------------------------------- ---- new test ---- 1772747648.193 sable_services uid=1001 1772747648.193 sable_ircd uid=1001 1772747648.195 sable_services #x1B[2m2026-03-05T21:54:08.194423Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.History"), address: "127.0.0.1:60745", fingerprint: "4a2a95d286514b6b3bbc01ce0b75dbd9b988d16c" } 1772747648.195 sable_services #x1B[2m2026-03-05T21:54:08.194711Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Could not connect to 127.0.0.1:60745. Last error: I/O error: Connection refused (os error 111) 1772747648.195 sable_services #x1B[2m2026-03-05T21:54:08.194769Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.History#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mI/O error: Connection refused (os error 111) 1772747648.199 sable_ircd #x1B[2m2026-03-05T21:54:08.198765Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Server"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock() my clock=EventClock() 1772747648.199 sable_ircd #x1B[2m2026-03-05T21:54:08.199328Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.199679Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, clock: EventClock(), target: Server(ServerId(1)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Server"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(1) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.199839Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] }) 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.199873Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, change: NewServer(NewServer { server: ServerId(1) }), users_to_notify: [] } 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.199908Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.199929Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350240268288)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.200025Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350248656897)), timestamp: 1772747648, clock: EventClock(1 => 817515350240268288), target: Server(ServerId(1)), details: ServerPing(ServerPing { ts: 1772747648 }) }; event clock=EventClock(1 => 817515350240268288) my clock=EventClock(1 => 817515350240268288) 1772747648.200 sable_ircd #x1B[2m2026-03-05T21:54:08.200081Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747648.201 sable_ircd #x1B[2m2026-03-05T21:54:08.200286Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350248656897)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.201 sable_ircd #x1B[2m2026-03-05T21:54:08.200322Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350248656897)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.201 sable_ircd #x1B[2m2026-03-05T21:54:08.200872Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from reap_preclients_timer 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.286757Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 1), remote_addr: 127.0.0.1, tls_info: None } 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.286946Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.287020Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.287110Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): :My.Little.Server NOTICE * :*** Looking up your hostname 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.287293Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.287 sable_ircd #x1B[2m2026-03-05T21:54:08.287381Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT :chkport" 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.287526Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 1): ERROR :Client quit 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.287647Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 1)) 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.287691Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 1) 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.288306Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 1) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.288375Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1772747648.288 sable_ircd #x1B[2m2026-03-05T21:54:08.288447Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.299 sable_services #x1B[2m2026-03-05T21:54:08.299199Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting network state from PeerConfig { name: ServerName("My.Little.Server"), address: "127.0.0.1:47905", fingerprint: "5264ab93242d734b90c3240e1bd2034c23e29119" } 1772747648.300 sable_services #x1B[2m2026-03-05T21:54:08.299426Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: GetNetworkState } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747648.305 sable_ircd #x1B[2m2026-03-05T21:54:08.304555Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::node#x1B[0m#x1B[2m:#x1B[0m Server got state export request; sending 1772747648.308 chkSvs: connects to server. 1772747648.308 chkSvs -> S: NICK chkSvs 1772747648.308 chkSvs -> S: USER chk chk chk chk 1772747648.308 sable_ircd #x1B[2m2026-03-05T21:54:08.308219Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 2), remote_addr: 127.0.0.1, tls_info: None } 1772747648.308 sable_ircd #x1B[2m2026-03-05T21:54:08.308324Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.308 sable_ircd #x1B[2m2026-03-05T21:54:08.308404Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308471Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Looking up your hostname 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308628Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308686Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK chkSvs" 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308838Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 485, tv_nsec: 645111758 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308904Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.308961Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.309011Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER chk chk chk chk" 1772747648.309 sable_ircd #x1B[2m2026-03-05T21:54:08.309099Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 485, tv_nsec: 645111758 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309625Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309669Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 2): 127.0.0.1/Some(Hostname("localhost")) 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309697Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309719Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 485, tv_nsec: 645111758 }, attach_user_id: OnceLock(), user: OnceLock(Username("chk")), extra_user_params: OnceLock(("chk", "chk")), nick: OnceLock(Nickname("chkSvs")), realname: OnceLock(Realname("chk")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309760Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 2)) 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.309975Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }; event clock=EventClock(1 => 817515350248656897) my clock=EventClock(1 => 817515350248656897) 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.310081Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.310327Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 1) }), users_to_notify: [] }) 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.310392Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 1) }), users_to_notify: [] } 1772747648.310 sable_ircd #x1B[2m2026-03-05T21:54:08.310451Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), connection: UserConnectionId(Snowflake(817515350705836033)) }), users_to_notify: [] }) 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310484Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), connection: UserConnectionId(Snowflake(817515350705836033)) }), users_to_notify: [] } 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310550Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310594Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310643Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 003 chkSvs :This server was created 2026-03-05 21:54:08.310626547 UTC 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310688Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310754Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310793Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server 422 chkSvs :MOTD File is missing 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310829Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :chkSvs!chk@localhost MODE chkSvs + 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310869Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310944Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.311 sable_ircd #x1B[2m2026-03-05T21:54:08.310979Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.346 sable_services #x1B[2m2026-03-05T21:54:08.345951Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Bootstrap message: Message { source_server: (ServerId(1), 1772747648), content: NetworkState(Network { nick_bindings: {}, historic_nick_users: HistoricNickStore { data: {} }, users: {}, historic_users: HistoricUserStore { users: {} }, user_connections: {}, channels: {}, list_mode_entries: {}, channel_topics: {}, channel_invites: {}, memberships: {}, messages: {}, servers: {ServerId(1): Server { id: ServerId(1), epoch: 1772747648, name: ServerName("My.Little.Server"), last_ping: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }}, network_bans: BanRepository { pre_registration_bans: {}, new_connection_bans: {}, pre_sasl_bans: {}, pre_registration_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: ["", "", "", "", "", ""], uint64: [], regex: [] }, fields: {"tls": (0, Boolean(_)), "host": (2, String(_)), "user_param_2": (1, String(_)), "ip": (0, Ip(_)), "realname": (4, String(_)), "user": (0, String(_)), "user_param_1": (3, String(_)), "nick": (5, String(_))} }, new_connection_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [], uint64: [], regex: [] }, fields: {"ip": (0, Ip(_)), "tls": (0, Boolean(_))} }, pre_sasl_engine: Engine { operations: [], constants: Scratch { boolean: [], cidr: [], int64: [], ip: [], string: [], uint64: [], regex: [] }, reference_dynamics: Scratch { boolean: [false], cidr: [], int64: [], ip: [0.0.0.0], string: [""], uint64: [], regex: [] }, fields: {"mechanism": (0, String(_)), "tls": (0, Boolean(_)), "ip": (0, Ip(_))} } }, audit_log: {}, accounts: {}, nick_registrations: {}, channel_registrations: {}, channel_accesses: {}, channel_roles: {}, current_services: None, current_history_server_id: None, config: NetworkConfig { opers: [OperConfig { name: "operuser", hash: "$6$z5yA.OfGliDoi/R2$BgSsguS6bxAsPSCygDisgDw5JZuo5.88eU3Hyc7/4OaNpeKIxWGjOggeHzOl0xLiZg1vfwxXjOTFN14wG5vNI." }], debug_mode: true, default_roles: {BuiltinVoice: ChannelAccessSet(4296081441), BuiltinAll: ChannelAccessSet(1114112), BuiltinOp: ChannelAccessSet(222192934775)}, alias_users: [AliasUser { nick: Nickname("ChanServ"), user: Username("ChanServ"), host: Hostname("services."), realname: Realname("Channel services compatibility layer"), command_alias: "CS" }, AliasUser { nick: Nickname("NickServ"), user: Username("NickServ"), host: Hostname("services."), realname: Realname("Account services compatibility layer"), command_alias: "NS" }], object_expiry: 60, pingout_duration: 600 }, clock: EventClock(1 => 817515350248656897), cache_default_channel_roles: OnceLock(), alias_users: OnceLock() }) } 1772747648.346 sable_services #x1B[2m2026-03-05T21:54:08.346102Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_to_network#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Server 1772747648.346 sable_services #x1B[2m2026-03-05T21:54:08.346218Z#x1B[0m #x1B[33m WARN#x1B[0m #x1B[2msable_services::database::jsonfile#x1B[0m#x1B[2m:#x1B[0m Couldn't open database file, starting from empty 1772747648.347 sable_services #x1B[2m2026-03-05T21:54:08.346767Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 817515350248656897) my clock=EventClock(1 => 817515350248656897) 1772747648.347 sable_services #x1B[2m2026-03-05T21:54:08.347064Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747648.349 sable_services #x1B[2m2026-03-05T21:54:08.348767Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }; event clock=EventClock(1 => 817515350248656897, 99 => 817515350861426688) my clock=EventClock(1 => 817515350248656897, 99 => 817515350861426688) 1772747648.349 sable_services #x1B[2m2026-03-05T21:54:08.349370Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747648.353 sable_services #x1B[2m2026-03-05T21:54:08.353086Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1772747648.353 sable_services #x1B[2m2026-03-05T21:54:08.353422Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 817515350248656897, 99 => 817515350869815297) my clock=EventClock(1 => 817515350248656897, 99 => 817515350869815297) 1772747648.354 sable_services #x1B[2m2026-03-05T21:54:08.353683Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747648.354 sable_ircd #x1B[2m2026-03-05T21:54:08.354003Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }; event clock=EventClock(1 => 817515350248656897, 99 => 817515350861426688) my clock=EventClock(1 => 817515350705836034) 1772747648.354 sable_ircd #x1B[2m2026-03-05T21:54:08.354104Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(817515350861426688))] 1772747648.354 sable_ircd #x1B[2m2026-03-05T21:54:08.354163Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.389662Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }; event clock=EventClock(1 => 817515350248656897) my clock=EventClock(1 => 817515350705836034) 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.389731Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350861426688), target: Server(ServerId(99)), details: ServerPing(ServerPing { ts: 1772747648 }) } 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.389782Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390015Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun#x1B[0m#x1B[2m:#x1B[0m#x1B[1mapply_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mevent#x1B[0m#x1B[2m=#x1B[0mEvent { id: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: Server(ServerId(99)), details: NewServer(NewServer { epoch: 1772747648, name: ServerName("My.Little.Services"), ts: 1772747648, flags: (empty), version: "sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432" }) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_server#x1B[0m#x1B[1m{#x1B[0m#x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mNewServer { server: ServerId(99) }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m enabling peer My.Little.Services 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390204Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] }) 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390238Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, change: NewServer(NewServer { server: ServerId(99) }), users_to_notify: [] } 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390282Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390304Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350861426688)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390357Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.390 sable_ircd #x1B[2m2026-03-05T21:54:08.390388Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350869815297)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.396 sable_services #x1B[2m2026-03-05T21:54:08.395578Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: GetEvent([EventId(Snowflake(817515350861426688))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(817515350861426688))] 1772747648.396 sable_services #x1B[2m2026-03-05T21:54:08.395620Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: GetEvent([EventId(Snowflake(817515350861426688))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [] 1772747648.397 sable_ircd #x1B[2m2026-03-05T21:54:08.396644Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }; event clock=EventClock(1 => 817515350248656897, 99 => 817515350869815297) my clock=EventClock(1 => 817515350705836034, 99 => 817515350869815297) 1772747648.397 sable_ircd #x1B[2m2026-03-05T21:54:08.396998Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897, 99 => 817515350869815297), target: Server(ServerId(99)), details: IntroduceServicesServer(IntroduceServicesServer { sasl_mechanisms: ["PLAIN"] }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747648.401 sable_ircd #x1B[2m2026-03-05T21:54:08.400667Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] }) 1772747648.401 sable_ircd #x1B[2m2026-03-05T21:54:08.400709Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, change: ServicesUpdate(ServicesUpdate), users_to_notify: [] } 1772747648.401 sable_ircd #x1B[2m2026-03-05T21:54:08.400808Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747648.401 sable_ircd #x1B[2m2026-03-05T21:54:08.400845Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515350890786818)), timestamp: 1772747648, change: EventComplete(EventComplete), users_to_notify: [] } 1772747648.408 S -> chkSvs: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747648.408 S -> chkSvs: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747648.408 S -> chkSvs: :My.Little.Server 001 chkSvs :Welcome to the test Internet Relay Chat network, chkSvs 1772747648.408 S -> chkSvs: :My.Little.Server 002 chkSvs :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747648.408 S -> chkSvs: :My.Little.Server 003 chkSvs :This server was created 2026-03-05 21:54:08.310626547 UTC 1772747648.408 S -> chkSvs: :My.Little.Server 004 chkSvs My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747648.408 S -> chkSvs: :My.Little.Server 005 chkSvs EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1772747648.408 S -> chkSvs: :My.Little.Server 422 chkSvs :MOTD File is missing 1772747648.408 S -> chkSvs: :chkSvs!chk@localhost MODE chkSvs + 1772747648.408 S -> chkSvs: :My.Little.Server NOTICE chkSvs :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747648.408 chkSvs -> S: CAP LS 302 1772747648.409 sable_ircd #x1B[2m2026-03-05T21:54:08.408615Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.409 sable_ircd #x1B[2m2026-03-05T21:54:08.408657Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP LS 302" 1772747648.409 sable_ircd #x1B[2m2026-03-05T21:54:08.408755Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1772747648.437 sable_ircd #x1B[2m2026-03-05T21:54:08.436612Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: BulkEvents([]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [] 1772747648.458 chkSvs -> S: PING synchronize485.795061861 1772747648.458 S -> chkSvs: :My.Little.Server CAP * LS :message-tags server-time echo-message sasl=PLAIN,EXTERNAL batch labeled-response userhost-in-names away-notify account-tag multi-prefix draft/chathistory sable.libera.chat/persistent-session draft/account-registration draft/channel-rename 1772747648.459 sable_ircd #x1B[2m2026-03-05T21:54:08.458798Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.459 sable_ircd #x1B[2m2026-03-05T21:54:08.458860Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize485.795061861" 1772747648.459 sable_ircd #x1B[2m2026-03-05T21:54:08.458989Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): :My.Little.Server PONG My.Little.Server :synchronize485.795061861 1772747648.459 S -> chkSvs: :My.Little.Server PONG My.Little.Server :synchronize485.795061861 1772747648.459 chkSvs -> S: QUIT 1772747648.459 chkSvs -> S: PING synchronize485.796021555 1772747648.460 sable_ircd #x1B[2m2026-03-05T21:54:08.459568Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.460 sable_ircd #x1B[2m2026-03-05T21:54:08.459620Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT" 1772747648.460 sable_ircd #x1B[2m2026-03-05T21:54:08.459717Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747648.460 sable_ircd #x1B[2m2026-03-05T21:54:08.459767Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize485.796021555" 1772747648.558 sable_history #x1B[2m2027-03-05T22:33:23.593428Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949796800422944814)), timestamp: 1804286003, clock: EventClock(1 => 949786721300516886, 50 => 949796548563378221, 99 => 949786724434063364), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804286003 }) }; event clock=EventClock(1 => 949786721300516886, 50 => 949796548563378221, 99 => 949786724434063364) my clock=EventClock(1 => 949786721300516886, 50 => 949796548563378221, 99 => 949786724434063364) 1772747648.558 sable_history #x1B[2m2027-03-05T22:33:23.595069Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747649.213 sable_ircd #x1B[2m2026-03-05T21:54:09.212762Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 2): ERROR :Client quit 1772747649.213 sable_ircd #x1B[2m2026-03-05T21:54:09.212919Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 2)) 1772747649.213 sable_ircd #x1B[2m2026-03-05T21:54:09.212957Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 2) 1772747649.213 sable_ircd #x1B[2m2026-03-05T21:54:09.213124Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817515350705836034, 99 => 817515350890786818) my clock=EventClock(1 => 817515350705836034, 99 => 817515350890786818) 1772747649.214 S -> chkSvs: ERROR :Client quit 1772747649.214 chkSvs: disconnects from server. 1772747649.214 1: connects to server. 1772747649.214 1 -> S: NICK jilles 1772747649.215 1 -> S: USER r e g :user 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.213478Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.213781Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 2) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.213879Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.214639Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 3), remote_addr: 127.0.0.1, tls_info: None } 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.214759Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.214811Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.214864Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Looking up your hostname 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.215041Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.215095Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"NICK jilles" 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.215245Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 486, tv_nsec: 551514473 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(Nickname("jilles")), realname: OnceLock(), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747649.215 sable_ircd #x1B[2m2026-03-05T21:54:09.215322Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1772747649.215 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747649.216 sable_ircd #x1B[2m2026-03-05T21:54:09.215622Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.216 sable_ircd #x1B[2m2026-03-05T21:54:09.215673Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"USER r e g :user" 1772747649.216 sable_ircd #x1B[2m2026-03-05T21:54:09.215762Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 486, tv_nsec: 551514473 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216250Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817515354497486851, 99 => 817515350890786818) my clock=EventClock(1 => 817515354497486851, 99 => 817515350890786818) 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216673Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(817515350705836033)), user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 } }), users_to_notify: [] }) 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216718Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), connection: UserConnection { id: UserConnectionId(Snowflake(817515350705836033)), user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 } }), users_to_notify: [] } 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216781Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216814Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] } 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.216930Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.217080Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.217203Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 3): 127.0.0.1/Some(Hostname("localhost")) 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.217268Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747649.217 sable_ircd #x1B[2m2026-03-05T21:54:09.217320Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 486, tv_nsec: 551514473 }, attach_user_id: OnceLock(), user: OnceLock(Username("r")), extra_user_params: OnceLock(("e", "g")), nick: OnceLock(Nickname("jilles")), realname: OnceLock(Realname("user")), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 0 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mtrue #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747649.218 sable_ircd #x1B[2m2026-03-05T21:54:09.217465Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mRegisterClient(ConnectionId(ListenerId(0), 3)) 1772747649.218 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747649.219 sable_ircd #x1B[2m2026-03-05T21:54:09.219273Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }; event clock=EventClock(1 => 817515354510069764, 99 => 817515350890786818) my clock=EventClock(1 => 817515354510069764, 99 => 817515350890786818) 1772747649.220 sable_ircd #x1B[2m2026-03-05T21:54:09.219657Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.220 sable_ircd #x1B[2m2026-03-05T21:54:09.219801Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1772747649.220 sable_ircd #x1B[2m2026-03-05T21:54:09.219845Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817515350705836032)), 2), nickname: Nickname("chkSvs"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1772747649.220 sable_ircd #x1B[2m2026-03-05T21:54:09.219919Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747649.220 sable_ircd #x1B[2m2026-03-05T21:54:09.219954Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] } 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.221757Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 1) }), users_to_notify: [] }) 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.221804Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: NewUser(NewUser { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 1) }), users_to_notify: [] } 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.221877Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 2), connection: UserConnectionId(Snowflake(817515354514264067)) }), users_to_notify: [] }) 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.221924Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: NewUserConnection(NewUserConnection { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 2), connection: UserConnectionId(Snowflake(817515354514264067)) }), users_to_notify: [] } 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222005Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222048Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222072Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 003 jilles :This server was created 2026-03-05 21:54:09.222064348 UTC 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222091Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222113Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222132Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server 422 jilles :MOTD File is missing 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222151Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :jilles!r@localhost MODE jilles + 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222167Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222205Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747649.222 sable_ircd #x1B[2m2026-03-05T21:54:09.222226Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] } 1772747649.222 S -> 1: :My.Little.Server 001 jilles :Welcome to the test Internet Relay Chat network, jilles 1772747649.223 S -> 1: :My.Little.Server 002 jilles :Your host is My.Little.Server, running version sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 1772747649.259 sable_services #x1B[2m2026-03-05T21:54:09.258730Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817515350705836034, 99 => 817515350890786818) my clock=EventClock(1 => 817515350248656897, 99 => 817515350890786818) 1772747649.259 sable_services #x1B[2m2026-03-05T21:54:09.258796Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(817515350705836034))] 1772747649.259 sable_services #x1B[2m2026-03-05T21:54:09.259159Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747649.261 sable_services #x1B[2m2026-03-05T21:54:09.261208Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817515354497486851, 99 => 817515350890786818) my clock=EventClock(1 => 817515350248656897, 99 => 817515350890786818) 1772747649.261 sable_services #x1B[2m2026-03-05T21:54:09.261298Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(817515354497486851))] 1772747649.262 sable_services #x1B[2m2026-03-05T21:54:09.261685Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747649.264 sable_services #x1B[2m2026-03-05T21:54:09.263961Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }; event clock=EventClock(1 => 817515354510069764, 99 => 817515350890786818) my clock=EventClock(1 => 817515350248656897, 99 => 817515350890786818) 1772747649.264 sable_services #x1B[2m2026-03-05T21:54:09.264061Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(817515354510069764))] 1772747649.264 sable_services #x1B[2m2026-03-05T21:54:09.264354Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747649.300 sable_ircd #x1B[2m2026-03-05T21:54:09.299764Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515350705836034))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(817515350705836034))] 1772747649.300 sable_ircd #x1B[2m2026-03-05T21:54:09.299823Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515350705836034))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }] 1772747649.303 sable_ircd #x1B[2m2026-03-05T21:54:09.302520Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515354497486851))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(817515354497486851))] 1772747649.303 sable_ircd #x1B[2m2026-03-05T21:54:09.302572Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515354497486851))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }] 1772747649.306 sable_ircd #x1B[2m2026-03-05T21:54:09.305499Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515354510069764))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(817515354510069764))] 1772747649.306 sable_ircd #x1B[2m2026-03-05T21:54:09.305533Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515354510069764))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1772747649.323 1 -> S: PING synchronize486.659307038 1772747649.323 S -> 1: :My.Little.Server 003 jilles :This server was created 2026-03-05 21:54:09.222064348 UTC 1772747649.323 S -> 1: :My.Little.Server 004 jilles My.Little.Server sable-0.1.0-70e61b4cc015537d8906da5286f062a8199fb432 ioZ ntsim bqeIkov 1772747649.323 S -> 1: :My.Little.Server 005 jilles EXCEPTS INVEX FNC UTF8ONLY MONITOR=64 CASEMAPPING=ascii CLIENTTAGDENY=* HOSTLEN=64 NICKLEN=15 USERLEN=10 CHANMODES=bqeI,k,,ntsim MSGREFTYPES=timestamp PREFIX=(ov)@+ :are supported by this server 1772747649.323 S -> 1: :My.Little.Server 422 jilles :MOTD File is missing 1772747649.323 S -> 1: :jilles!r@localhost MODE jilles + 1772747649.323 S -> 1: :My.Little.Server NOTICE jilles :The network is currently running in debug mode. Do not send any sensitive information such as passwords. 1772747649.323 sable_ircd #x1B[2m2026-03-05T21:54:09.323186Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.323 sable_ircd #x1B[2m2026-03-05T21:54:09.323249Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize486.659307038" 1772747649.323 sable_ircd #x1B[2m2026-03-05T21:54:09.323409Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize486.659307038 1772747649.324 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize486.659307038 1772747649.324 1 -> S: REGISTER * * sesame 1772747649.324 sable_ircd #x1B[2m2026-03-05T21:54:09.324061Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.324 sable_ircd #x1B[2m2026-03-05T21:54:09.324102Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"REGISTER * * sesame" 1772747649.324 sable_ircd #x1B[2m2026-03-05T21:54:09.324330Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:48663", fingerprint: "c65af79824ec74b717c0d7315280c77db543439a" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) } 1772747649.325 sable_ircd #x1B[2m2026-03-05T21:54:09.324606Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(RegisterUser(Nickname("jilles"), "sesame")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.327 sable_ircd #x1B[2m2026-03-05T21:54:09.326730Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(26) }) 1772747649.341 sable_services #x1B[2m2026-03-05T21:54:09.340787Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }] 1772747649.341 sable_services #x1B[2m2026-03-05T21:54:09.340903Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }; event clock=EventClock(1 => 817515350248656897) my clock=EventClock(1 => 817515350248656897, 99 => 817515350890786818) 1772747649.341 sable_services #x1B[2m2026-03-05T21:54:09.341046Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) } 1772747649.341 sable_services #x1B[2m2026-03-05T21:54:09.341124Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1772747649.341 sable_services #x1B[2m2026-03-05T21:54:09.341219Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515350705836034)), timestamp: 1772747648, clock: EventClock(1 => 817515350248656897), target: User(UserId(Snowflake(817515350705836032))), details: NewUser(NewUser { nickname: Nickname("chkSvs"), username: Username("chk"), visible_hostname: Hostname("localhost"), realname: Realname("chk"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515350705836033)), NewUserConnection { user: UserId(Snowflake(817515350705836032)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747648 })) }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mfalse#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(817515354522652677)), timestamp: 1772747649, clock: EventClock(1 => 817515354510069764, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: NewUser(NewUser { nickname: Nickname("jilles"), username: Username("r"), visible_hostname: Hostname("localhost"), realname: Realname("user"), mode: UserMode { modes: UserModeSet(0) }, server: ServerId(1), account: None, initial_connection: Some((UserConnectionId(Snowflake(817515354514264067)), NewUserConnection { user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 })) }) } 1772747649.344 sable_services #x1B[2m2026-03-05T21:54:09.343571Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(817515354497486851)), timestamp: 1772747649, clock: EventClock(1 => 817515350705836034, 99 => 817515350890786818), target: UserConnection(UserConnectionId(Snowflake(817515350705836033))), details: UserDisconnect(UserDisconnect) }] 1772747649.347 sable_services #x1B[2m2026-03-05T21:54:09.346548Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(817515354510069764)), timestamp: 1772747649, clock: EventClock(1 => 817515354497486851, 99 => 817515350890786818), target: User(UserId(Snowflake(817515350705836032))), details: UserQuit(UserQuit { message: "Client Quit" }) }] 1772747649.369 sable_services #x1B[2m2026-03-05T21:54:09.368746Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(RegisterUser(Nickname("jilles"), "sesame")) 1772747649.369 sable_services #x1B[2m2026-03-05T21:54:09.368786Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got register request #x1B[3maccount_name#x1B[0m#x1B[2m=#x1B[0mNickname("jilles") 1772747649.375 sable_services #x1B[2m2026-03-05T21:54:09.374503Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server::command::user_commands#x1B[0m#x1B[2m:#x1B[0m Successfully created account #x1B[3mnew_account#x1B[0m#x1B[2m=#x1B[0mAccount { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] } 1772747649.375 sable_services #x1B[2m2026-03-05T21:54:09.374705Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) my clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) 1772747649.375 sable_services #x1B[2m2026-03-05T21:54:09.375015Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.415609Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: TargetedMessageResponse(Services(LogUserIn(AccountId(Snowflake(817515355148005376))))) } } 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.415832Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): REGISTER SUCCESS jilles :You have successfully registered 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.415887Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.415918Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mStateChange(User(UserId(Snowflake(817515354514264066))), UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) })) 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.416049Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }; event clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) my clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) 1772747649.416 sable_ircd #x1B[2m2026-03-05T21:54:09.416372Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.418 sable_ircd #x1B[2m2026-03-05T21:54:09.418176Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }; event clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) my clock=EventClock(1 => 817515355348930566, 99 => 817515350890786818) 1772747649.419 sable_ircd #x1B[2m2026-03-05T21:54:09.418811Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: Account(AccountId(Snowflake(817515355148005376))), details: AccountUpdate(AccountUpdate { data: Some(Account { id: AccountId(Snowflake(817515355148005376)), name: Nickname("jilles"), authorised_fingerprints: [] }) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.422761Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), old_account: None, new_account: Some(AccountId(Snowflake(817515355148005376))) }), users_to_notify: [] }) 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.422813Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, change: UserLoginChange(UserLoginChange { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), old_account: None, new_account: Some(AccountId(Snowflake(817515355148005376))) }), users_to_notify: [] } 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.422900Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.422944Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] } 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.423020Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747649.423 sable_ircd #x1B[2m2026-03-05T21:54:09.423061Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515355173171203)), timestamp: 1772747649, change: EventComplete(EventComplete), users_to_notify: [] } 1772747649.460 sable_services #x1B[2m2026-03-05T21:54:09.459718Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }; event clock=EventClock(1 => 817515354522652677, 99 => 817515350890786818) my clock=EventClock(1 => 817515354522652677, 99 => 817515355173171203) 1772747649.460 sable_services #x1B[2m2026-03-05T21:54:09.460081Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515355348930566)), timestamp: 1772747649, clock: EventClock(1 => 817515354522652677, 99 => 817515350890786818), target: User(UserId(Snowflake(817515354514264066))), details: UserLogin(UserLogin { account: Some(AccountId(Snowflake(817515355148005376))) }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747649.485 sable_history #x1B[2m2027-03-05T22:36:12.459957Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949797508702478385)), timestamp: 1804286172, clock: EventClock(1 => 949786674810851350, 50 => 949797257044238384, 99 => 949786678212833284), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804286172 }) }; event clock=EventClock(1 => 949786674810851350, 50 => 949797257044238384, 99 => 949786678212833284) my clock=EventClock(1 => 949786674810851350, 50 => 949797257044238384, 99 => 949786678212833284) 1772747649.485 sable_history #x1B[2m2027-03-05T22:36:12.461594Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747649.524 1 -> S: PING synchronize486.86065927 1772747649.524 S -> 1: REGISTER SUCCESS jilles :You have successfully registered 1772747649.525 sable_ircd #x1B[2m2026-03-05T21:54:09.524562Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747649.525 sable_ircd #x1B[2m2026-03-05T21:54:09.524633Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize486.86065927" 1772747649.852 sable_history #x1B[2m2027-03-05T22:25:56.661304Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949794925854269478)), timestamp: 1804285556, clock: EventClock(1 => 949787112654245921, 50 => 949794674196029477, 99 => 949787117096415237), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285556 }) }; event clock=EventClock(1 => 949787112654245921, 50 => 949794674196029477, 99 => 949787117096415237) my clock=EventClock(1 => 949787112654245921, 50 => 949794674196029477, 99 => 949787117096415237) 1772747649.852 sable_history #x1B[2m2027-03-05T22:25:56.662986Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747650.028 sable_ircd #x1B[2m2026-03-05T21:54:10.027852Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): :My.Little.Server PONG My.Little.Server :synchronize486.86065927 1772747650.028 S -> 1: :My.Little.Server PONG My.Little.Server :synchronize486.86065927 1772747650.028 1 -> S: QUIT 1772747650.029 sable_ircd #x1B[2m2026-03-05T21:54:10.028609Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747650.029 sable_ircd #x1B[2m2026-03-05T21:54:10.028653Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"QUIT" 1772747650.110 sable_history #x1B[2m2027-03-05T22:39:01.007593Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949798215639834676)), timestamp: 1804286341, clock: EventClock(1 => 949786627163557910, 50 => 949797963985788979, 99 => 949786630502625284), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804286341 }) }; event clock=EventClock(1 => 949786627163557910, 50 => 949797963985788979, 99 => 949786630502625284) my clock=EventClock(1 => 949786627163557910, 50 => 949797963985788979, 99 => 949786630502625284) 1772747650.110 sable_history #x1B[2m2027-03-05T22:39:01.008997Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747650.129 1 -> S: PING synchronize487.46512953 1772747650.129 sable_ircd #x1B[2m2026-03-05T21:54:10.129052Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747650.129 sable_ircd #x1B[2m2026-03-05T21:54:10.129129Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"PING synchronize487.46512953" 1772747650.211 sable_history #x1B[2m2027-03-05T22:23:11.037357Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949794231176863778)), timestamp: 1804285391, clock: EventClock(1 => 949786416022294531, 50 => 949793979522818081), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285391 }) }; event clock=EventClock(1 => 949786416022294531, 50 => 949793979522818081) my clock=EventClock(1 => 949786416022294531, 50 => 949793979522818081) 1772747650.211 sable_history #x1B[2m2027-03-05T22:23:11.039381Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747650.649 sable_history #x1B[2m2027-03-05T22:23:09.562052Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949794224990265378)), timestamp: 1804285389, clock: EventClock(1 => 949786411253370881, 50 => 949793973332025377), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285389 }) }; event clock=EventClock(1 => 949786411253370881, 50 => 949793973332025377) my clock=EventClock(1 => 949786411253370881, 50 => 949793973332025377) 1772747650.649 sable_history #x1B[2m2027-03-05T22:23:09.564034Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747650.728 sable_history #x1B[2m2027-03-05T22:41:58.431413Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949798959810027575)), timestamp: 1804286518, clock: EventClock(1 => 949786576752218129, 50 => 949798708151787574, 99 => 949786583388008453), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804286518 }) }; event clock=EventClock(1 => 949786576752218129, 50 => 949798708151787574, 99 => 949786583388008453) my clock=EventClock(1 => 949786576752218129, 50 => 949798708151787574, 99 => 949786583388008453) 1772747650.728 sable_history #x1B[2m2027-03-05T22:41:58.432966Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747650.893 sable_history #x1B[2m2027-03-05T22:28:45.799603Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949795635270459433)), timestamp: 1804285725, clock: EventClock(1 => 949786815001268246, 50 => 949795383612219432, 99 => 949786818277421060), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285725 }) }; event clock=EventClock(1 => 949786815001268246, 50 => 949795383612219432, 99 => 949786818277421060) my clock=EventClock(1 => 949786815001268246, 50 => 949795383612219432, 99 => 949786818277421060) 1772747650.893 sable_history #x1B[2m2027-03-05T22:28:45.801023Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747651.096 sable_history #x1B[2m2027-03-05T22:23:09.968503Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(949794226693152802)), timestamp: 1804285389, clock: EventClock(1 => 949786413140807681, 50 => 949793975039107105), target: Server(ServerId(50)), details: ServerPing(ServerPing { ts: 1804285389 }) }; event clock=EventClock(1 => 949786413140807681, 50 => 949793975039107105) my clock=EventClock(1 => 949786413140807681, 50 => 949793975039107105) 1772747651.097 sable_history #x1B[2m2027-03-05T22:23:09.970261Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m No peers available to propagate message 1772747651.129 1: waiting… 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.133506Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 3): ERROR :Client quit 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.133663Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mCloseConnection(ConnectionId(ListenerId(0), 3)) 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.133701Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::connection_collection#x1B[0m#x1B[2m:#x1B[0m Removing connection ConnectionId(ListenerId(0), 3) 1772747651.134 S -> 1: ERROR :Client quit 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.133911Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817515355348930566, 99 => 817515355173171203) my clock=EventClock(1 => 817515355348930566, 99 => 817515355173171203) 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.134171Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m Connection error #x1B[3mconnection#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 3) #x1B[3merror#x1B[0m#x1B[2m=#x1B[0mClosed 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.134261Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747651.134 sable_ircd #x1B[2m2026-03-05T21:54:11.134359Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747651.136 sable_ircd #x1B[2m2026-03-05T21:54:11.136285Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817515362550550535, 99 => 817515355173171203) my clock=EventClock(1 => 817515362550550535, 99 => 817515355173171203) 1772747651.137 sable_ircd #x1B[2m2026-03-05T21:54:11.136567Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747651.137 sable_ircd #x1B[2m2026-03-05T21:54:11.136712Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(817515354514264067)), user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 } }), users_to_notify: [] }) 1772747651.137 sable_ircd #x1B[2m2026-03-05T21:54:11.136796Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, change: UserConnectionDisconnected(UserConnectionDisconnected { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), connection: UserConnection { id: UserConnectionId(Snowflake(817515354514264067)), user: UserId(Snowflake(817515354514264066)), hostname: Hostname("localhost"), ip: 127.0.0.1, connection_time: 1772747649 } }), users_to_notify: [] } 1772747651.137 sable_ircd #x1B[2m2026-03-05T21:54:11.136891Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747651.137 sable_ircd #x1B[2m2026-03-05T21:54:11.136927Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, change: EventComplete(EventComplete), users_to_notify: [] } 1772747651.141 sable_ircd #x1B[2m2026-03-05T21:54:11.140612Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] }) 1772747651.141 sable_ircd #x1B[2m2026-03-05T21:54:11.140663Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, change: UserQuit(UserQuit { user: HistoricUserId(UserId(Snowflake(817515354514264066)), 3), nickname: Nickname("jilles"), message: "Client Quit", memberships: [] }), users_to_notify: [] } 1772747651.141 sable_ircd #x1B[2m2026-03-05T21:54:11.140726Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from history_receiver #x1B[3mres#x1B[0m#x1B[2m=#x1B[0mSome(NetworkHistoryUpdate { event: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, change: EventComplete(EventComplete), users_to_notify: [] }) 1772747651.141 sable_ircd #x1B[2m2026-03-05T21:54:11.140758Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server::update_handler#x1B[0m#x1B[2m:#x1B[0m Got history update #x1B[3mupdate#x1B[0m#x1B[2m=#x1B[0mNetworkHistoryUpdate { event: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, change: EventComplete(EventComplete), users_to_notify: [] } 1772747651.141 sable_services #x1B[2m2026-03-05T21:54:11.141136Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Deferring event Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }; event clock=EventClock(1 => 817515362550550535, 99 => 817515355173171203) my clock=EventClock(1 => 817515355348930566, 99 => 817515355173171203) 1772747651.141 sable_services #x1B[2m2026-03-05T21:54:11.141214Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Requesting missing IDs [EventId(Snowflake(817515362550550535))] 1772747651.142 sable_services #x1B[2m2026-03-05T21:54:11.141633Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747651.178 sable_services #x1B[2m2026-03-05T21:54:11.177638Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding event Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }; event clock=EventClock(1 => 817515355348930566, 99 => 817515355173171203) my clock=EventClock(1 => 817515355348930566, 99 => 817515355173171203) 1772747651.178 sable_services #x1B[2m2026-03-05T21:54:11.177700Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::eventlog#x1B[0m#x1B[2m:#x1B[0m Adding satisfied deferred event Event { id: EventId(Snowflake(817515362563133448)), timestamp: 1772747651, clock: EventClock(1 => 817515362550550535, 99 => 817515355173171203), target: User(UserId(Snowflake(817515354514264066))), details: UserQuit(UserQuit { message: "Client Quit" }) } 1772747651.178 sable_services #x1B[2m2026-03-05T21:54:11.177985Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_new_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3mshould_propagate#x1B[0m#x1B[2m=#x1B[0mtrue#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(99), 1772747648), content: NewEvent(Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Server#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:47905 (127.0.0.1:47905) 1772747651.184 sable_ircd #x1B[2m2026-03-05T21:54:11.183518Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515362550550535))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got request for events [EventId(Snowflake(817515362550550535))] 1772747651.184 sable_ircd #x1B[2m2026-03-05T21:54:11.183565Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: GetEvent([EventId(Snowflake(817515362550550535))]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Sending events [Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }] 1772747651.225 sable_services #x1B[2m2026-03-05T21:54:11.224586Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mhandle_network_request#x1B[0m#x1B[1m{#x1B[0m#x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Server"), message: Message { source_server: (ServerId(1), 1772747648), content: BulkEvents([Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }]) } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got bulk events: [Event { id: EventId(Snowflake(817515362550550535)), timestamp: 1772747651, clock: EventClock(1 => 817515355348930566, 99 => 817515355173171203), target: UserConnection(UserConnectionId(Snowflake(817515354514264067))), details: UserDisconnect(UserDisconnect) }] 1772747651.234 1 -> S: PING synchronize488.570857935 1772747651.235 1: connects to server. 1772747651.235 1 -> S: CAP REQ :sasl 1772747651.235 sable_ircd #x1B[2m2026-03-05T21:54:11.235071Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mrun_communication_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2mclient_listener::listener_collection#x1B[0m#x1B[2m:#x1B[0m got new connection #x1B[3mdata#x1B[0m#x1B[2m=#x1B[0mConnectionData { id: ConnectionId(ListenerId(0), 4), remote_addr: 127.0.0.1, tls_info: None } 1772747651.235 sable_ircd #x1B[2m2026-03-05T21:54:11.235222Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747651.235 sable_ircd #x1B[2m2026-03-05T21:54:11.235283Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got new connection 1772747651.235 sable_ircd #x1B[2m2026-03-05T21:54:11.235375Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Looking up your hostname 1772747651.236 S -> 1: :My.Little.Server NOTICE * :*** Looking up your hostname 1772747651.236 sable_ircd #x1B[2m2026-03-05T21:54:11.235509Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747651.236 sable_ircd #x1B[2m2026-03-05T21:54:11.235552Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"CAP REQ :sasl" 1772747651.236 sable_ircd #x1B[2m2026-03-05T21:54:11.235674Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server CAP * ACK :sasl 1772747651.236 sable_ircd #x1B[2m2026-03-05T21:54:11.235722Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got pending CommandAction #x1B[3mact#x1B[0m#x1B[2m=#x1B[0mUpdateConnectionCaps(ConnectionId(ListenerId(0), 4), ClientCapabilitySet(8)) 1772747651.236 S -> 1: :My.Little.Server CAP * ACK :sasl 1772747651.236 1 -> S: AUTHENTICATE UNSUPPORTED_MECH 1772747651.236 sable_ircd #x1B[2m2026-03-05T21:54:11.236422Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from auth_events 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.236509Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m DNS lookup finished for ConnectionId(ListenerId(0), 4): 127.0.0.1/Some(Hostname("localhost")) 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.236560Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.236593Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m PreClient::can_register #x1B[3mself#x1B[0m#x1B[2m=#x1B[0mPreClient { connected_at: Instant { tv_sec: 488, tv_nsec: 571996869 }, attach_user_id: OnceLock(), user: OnceLock(), extra_user_params: OnceLock(), nick: OnceLock(), realname: OnceLock(), hostname: OnceLock(Hostname("localhost")), sasl_session: Mutex { data: None }, sasl_account: OnceLock(), progress_flags: 1 } #x1B[3mcan_register_new#x1B[0m#x1B[2m=#x1B[0mfalse #x1B[3mcan_attach#x1B[0m#x1B[2m=#x1B[0mfalse 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.236818Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from connection_events 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.236878Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m#x1B[1mprocess_connection_event#x1B[0m#x1B[1m{#x1B[0m#x1B[3msource#x1B[0m#x1B[2m=#x1B[0mConnectionId(ListenerId(0), 4)#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m Got message #x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0m"AUTHENTICATE UNSUPPORTED_MECH" 1772747651.237 S -> 1: :My.Little.Server NOTICE * :*** Found your hostname: localhost 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.237037Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::command::handlers::services::sasl#x1B[0m#x1B[2m:#x1B[0m Beginning new SASL session #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(817515362986758148)) 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.237158Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Found target peer, sending message #x1B[3mtarget#x1B[0m#x1B[2m=#x1B[0mPeerConfig { name: ServerName("My.Little.Services"), address: "127.0.0.1:48663", fingerprint: "c65af79824ec74b717c0d7315280c77db543439a" } #x1B[3mdetail#x1B[0m#x1B[2m=#x1B[0mTargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(817515362986758148)), "UNSUPPORTED_MECH")) } 1772747651.237 sable_ircd #x1B[2m2026-03-05T21:54:11.237390Z#x1B[0m #x1B[32m INFO#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m#x1B[1mdo_send_to#x1B[0m#x1B[1m{#x1B[0m#x1B[3mmsg#x1B[0m#x1B[2m=#x1B[0mMessage { source_server: (ServerId(1), 1772747648), content: TargetedMessage(TargetedMessage { source: ServerName("My.Little.Server"), target: ServerName("My.Little.Services"), via: [], content: Services(BeginAuthenticate(SaslSessionId(Snowflake(817515362986758148)), "UNSUPPORTED_MECH")) }) } #x1B[3mpeer#x1B[0m#x1B[2m=#x1B[0mMy.Little.Services#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Connected to 127.0.0.1:48663 (127.0.0.1:48663) 1772747651.239 sable_ircd #x1B[2m2026-03-05T21:54:11.239011Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got send result #x1B[3msend_result#x1B[0m#x1B[2m=#x1B[0mOk(JoinHandle { id: Id(35) }) 1772747651.280 sable_services #x1B[2m2026-03-05T21:54:11.279700Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got remote request #x1B[3mreq#x1B[0m#x1B[2m=#x1B[0mServices(BeginAuthenticate(SaslSessionId(Snowflake(817515362986758148)), "UNSUPPORTED_MECH")) 1772747651.280 sable_services #x1B[2m2026-03-05T21:54:11.279749Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1mhandle_remote_command#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_services::server#x1B[0m#x1B[2m:#x1B[0m Got begin authenticate #x1B[3msession#x1B[0m#x1B[2m=#x1B[0mSaslSessionId(Snowflake(817515362986758148)) #x1B[3mmechanism#x1B[0m#x1B[2m=#x1B[0m"UNSUPPORTED_MECH" 1772747651.322 sable_ircd #x1B[2m2026-03-05T21:54:11.321577Z#x1B[0m #x1B[34mDEBUG#x1B[0m #x1B[1msync_task#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::replicated_log#x1B[0m#x1B[2m:#x1B[0m Got targeted message response #x1B[3mresponse#x1B[0m#x1B[2m=#x1B[0mRequest { received_from: ServerName("My.Little.Services"), message: Message { source_server: (ServerId(99), 1772747648), content: TargetedMessageResponse(Services(Authenticate(Fail))) } } 1772747651.322 sable_ircd #x1B[2m2026-03-05T21:54:11.321773Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::client#x1B[0m#x1B[2m:#x1B[0m Sending to ConnectionId(ListenerId(0), 4): :My.Little.Server 904 * :SASL authentication failed 1772747651.322 sable_ircd #x1B[2m2026-03-05T21:54:11.321845Z#x1B[0m #x1B[35mTRACE#x1B[0m #x1B[1mdo_run#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_ircd::server#x1B[0m#x1B[2m:#x1B[0m ...from async_handlers 1772747651.322 S -> 1: :My.Little.Server 904 * :SASL authentication failed 1772747651.325 sable_ircd #x1B[2m2026-03-05T21:54:11.324572Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1772747651.325 sable_ircd #x1B[2m2026-03-05T21:54:11.324771Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[1mhandle_connection#x1B[0m#x1B[1m{#x1B[0m#x1B[3mconn#x1B[0m#x1B[2m=#x1B[0mPollEvented { io: Some(TcpStream { addr: 127.0.0.1:47905, peer: 127.0.0.1:47287, fd: 19 }) } #x1B[3mmessage_sender#x1B[0m#x1B[2m=#x1B[0mUnboundedSender { chan: Tx { inner: Chan { tx: Tx { block_tail: 0x5595f946e990, tail_position: 0 }, semaphore: Semaphore(0), rx_waker: AtomicWaker, tx_count: 2, rx_fields: "..." } } }#x1B[1m}#x1B[0m#x1B[2m:#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error handling message: I/O error: unexpected end of file 1772747651.325 sable_ircd #x1B[2m2026-03-05T21:54:11.324786Z#x1B[0m #x1B[31mERROR#x1B[0m #x1B[2msable_network::sync::network#x1B[0m#x1B[2m:#x1B[0m Error in outbound network sync connection: I/O error: unexpected end of file 1772747651.329 1: disconnects from server.